[INFO] cloning repository https://github.com/MBanucu/portable-pty-fixed
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/MBanucu/portable-pty-fixed" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FMBanucu%2Fportable-pty-fixed", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FMBanucu%2Fportable-pty-fixed'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 73fd9276bbf266f545b27ea8c1ef81d8a107e02f
[INFO] testing MBanucu/portable-pty-fixed against master#f9988fefd3add01f414f52b414308e7872622fee for pr-155114
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FMBanucu%2Fportable-pty-fixed" "/workspace/builds/worker-5-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/MBanucu/portable-pty-fixed
[INFO] finished tweaking git repo https://github.com/MBanucu/portable-pty-fixed
[INFO] tweaked toml for git repo https://github.com/MBanucu/portable-pty-fixed written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/MBanucu/portable-pty-fixed on toolchain f9988fefd3add01f414f52b414308e7872622fee
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+f9988fefd3add01f414f52b414308e7872622fee" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/MBanucu/portable-pty-fixed already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+f9988fefd3add01f414f52b414308e7872622fee" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded ntest_test_cases v0.9.5
[INFO] [stderr]   Downloaded ntest_timeout v0.9.5
[INFO] [stderr]   Downloaded serial2 v0.2.34
[INFO] [stderr]   Downloaded ntest v0.9.5
[INFO] [stderr]   Downloaded syn v2.0.116
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+f9988fefd3add01f414f52b414308e7872622fee" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8722fa56400c2923f211e82713a169c82c40cc480c41ade5a77cffe7ffa58f10
[INFO] running `Command { std: "docker" "start" "-a" "8722fa56400c2923f211e82713a169c82c40cc480c41ade5a77cffe7ffa58f10", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8722fa56400c2923f211e82713a169c82c40cc480c41ade5a77cffe7ffa58f10", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8722fa56400c2923f211e82713a169c82c40cc480c41ade5a77cffe7ffa58f10", kill_on_drop: false }`
[INFO] [stdout] 8722fa56400c2923f211e82713a169c82c40cc480c41ade5a77cffe7ffa58f10
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+f9988fefd3add01f414f52b414308e7872622fee" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 59c41c399577a5bd3532eb7f44c586b0a3a4fe778104c51575027ca0cf071541
[INFO] running `Command { std: "docker" "start" "-a" "59c41c399577a5bd3532eb7f44c586b0a3a4fe778104c51575027ca0cf071541", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling cfg_aliases v0.2.1
[INFO] [stderr]    Compiling anyhow v1.0.101
[INFO] [stderr]    Compiling shell-words v1.1.1
[INFO] [stderr]    Compiling downcast-rs v2.0.2
[INFO] [stderr]    Compiling syn v2.0.116
[INFO] [stderr]    Compiling nix v0.31.1
[INFO] [stderr]    Compiling serial2 v0.2.34
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling filedescriptor v0.8.3
[INFO] [stderr]    Compiling portable-pty v0.9.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.23s
[INFO] running `Command { std: "docker" "inspect" "59c41c399577a5bd3532eb7f44c586b0a3a4fe778104c51575027ca0cf071541", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "59c41c399577a5bd3532eb7f44c586b0a3a4fe778104c51575027ca0cf071541", kill_on_drop: false }`
[INFO] [stdout] 59c41c399577a5bd3532eb7f44c586b0a3a4fe778104c51575027ca0cf071541
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+f9988fefd3add01f414f52b414308e7872622fee" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5724a5ef32a7c26ec21bbc3adac59cf56779cebb47f40a5ae9c9cf4d3374e311
[INFO] running `Command { std: "docker" "start" "-a" "5724a5ef32a7c26ec21bbc3adac59cf56779cebb47f40a5ae9c9cf4d3374e311", kill_on_drop: false }`
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling futures-io v0.3.32
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling async-io v2.6.0
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling syn v2.0.116
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling regex-syntax v0.8.9
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling futures-lite v2.6.1
[INFO] [stderr]    Compiling piper v0.2.4
[INFO] [stderr]    Compiling nix v0.31.1
[INFO] [stderr]    Compiling concurrent-queue v2.5.0
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling event-listener v5.4.1
[INFO] [stderr]    Compiling event-listener-strategy v0.5.4
[INFO] [stderr]    Compiling async-executor v1.14.0
[INFO] [stderr]    Compiling async-channel v2.5.0
[INFO] [stderr]    Compiling async-lock v3.4.2
[INFO] [stderr]    Compiling blocking v1.6.2
[INFO] [stderr]    Compiling async-fs v2.2.0
[INFO] [stderr]    Compiling toml_parser v1.0.9+spec-1.1.0
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling toml_edit v0.23.10+spec-1.0.0
[INFO] [stderr]    Compiling proc-macro-crate v3.4.0
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling ntest_test_cases v0.9.5
[INFO] [stderr]    Compiling ntest_timeout v0.9.5
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling ntest v0.9.5
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling filedescriptor v0.8.3
[INFO] [stderr]    Compiling portable-pty v0.9.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling polling v3.11.0
[INFO] [stderr]    Compiling async-signal v0.2.13
[INFO] [stderr]    Compiling async-net v2.0.0
[INFO] [stderr]    Compiling async-process v2.5.0
[INFO] [stderr]    Compiling smol v2.0.2
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.54s
[INFO] running `Command { std: "docker" "inspect" "5724a5ef32a7c26ec21bbc3adac59cf56779cebb47f40a5ae9c9cf4d3374e311", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5724a5ef32a7c26ec21bbc3adac59cf56779cebb47f40a5ae9c9cf4d3374e311", kill_on_drop: false }`
[INFO] [stdout] 5724a5ef32a7c26ec21bbc3adac59cf56779cebb47f40a5ae9c9cf4d3374e311
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+f9988fefd3add01f414f52b414308e7872622fee" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a17215f3c653f51b416faa988685f1b8c46b36dd414577d0640e93cae6a47237
[INFO] running `Command { std: "docker" "start" "-a" "a17215f3c653f51b416faa988685f1b8c46b36dd414577d0640e93cae6a47237", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/portable_pty-dd43618c302ed65e)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test cmdbuilder::tests::test_cwd_relative ... ok
[INFO] [stdout] test cmdbuilder::tests::test_env ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration.rs (/opt/rustwide/target/debug/deps/integration-e9f55bd9cee32b2e)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test oneshot_command::test_echo::tests::test_echo ... ok
[INFO] [stdout] test interactive_session::test_bash::tests::test_bash_example ... ok
[INFO] [stdout] test interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit ... FAILED
[INFO] [stdout] test interactive_session::slow_reader_thread::tests::slow_reader_thread ... FAILED
[INFO] [stdout] test oneshot_command::test_kill::tests::test_wait_before_kill ... FAILED
[INFO] [stdout] test oneshot_command::test_kill::tests::test_kill ... FAILED
[INFO] [stdout] test oneshot_command::test_kill::tests::test_kill_return_value ... FAILED
[INFO] [stdout] test oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit stdout ----
[INFO] [stdout] Waiting for shell to exit...
[INFO] [stdout] 0	114	r
[INFO] [stdout] 1	111	o
[INFO] [stdout] 2	111	o
[INFO] [stdout] 3	116	t
[INFO] [stdout] 4	64	@
[INFO] [stdout] 5	97	a
[INFO] [stdout] 6	49	1
[INFO] [stdout] 7	55	7
[INFO] [stdout] 8	50	2
[INFO] [stdout] 9	49	1
[INFO] [stdout] 10	53	5
[INFO] [stdout] 11	102	f
[INFO] [stdout] 12	51	3
[INFO] [stdout] 13	99	c
[INFO] [stdout] 14	54	6
[INFO] [stdout] 15	53	5
[INFO] [stdout] 16	51	3
[INFO] [stdout] 17	58	:
[INFO] [stdout] 18	126	~
[INFO] [stdout] 19	35	#
[INFO] [stdout] 20	32	 
[INFO] [stdout] collected_output: root@a17215f3c653:~# 
[INFO] [stdout] 
[INFO] [stdout] thread '<unnamed>' (30) panicked at tests/interactive_session/try_reading_pipe_after_child_exit.rs:181:17:
[INFO] [stdout] timed out waiting on channel
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::trace_unsynchronized::<std[1209cfb42f6d497f]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5698ab7d6fda - std[1209cfb42f6d497f]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5698ab7d6fda - <<std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[4a92201981c6b77a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5698ab7ec3aa - <core[4a92201981c6b77a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5698ab7ec3aa - core[4a92201981c6b77a]::fmt::write
[INFO] [stdout]    6:     0x5698ab7dc572 - std[1209cfb42f6d497f]::io::default_write_fmt::<alloc[420bb310a727dfd7]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5698ab7dc572 - <alloc[420bb310a727dfd7]::vec::Vec<u8> as std[1209cfb42f6d497f]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5698ab7b4c5f - <std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5698ab7b4c5f - std[1209cfb42f6d497f]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5698ab7cf0a9 - std[1209cfb42f6d497f]::panicking::default_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5698ab70aacc - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5698ab70aacc - test[59e67a9bc0e119f1]::test_main_inner::<test[59e67a9bc0e119f1]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5698ab7cf322 - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5698ab7cf322 - std[1209cfb42f6d497f]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5698ab7b4d18 - std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5698ab7a9909 - std[1209cfb42f6d497f]::sys::backtrace::__rust_end_short_backtrace::<std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5698ab7b5b1d - __rustc[4effac393e9f3da6]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5698ab7ecb6c - core[4a92201981c6b77a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5698ab6e5798 - core[4a92201981c6b77a]::panicking::panic_display::<std[1209cfb42f6d497f]::sync::mpsc::RecvTimeoutError>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panicking.rs:259:5
[INFO] [stdout]   20:     0x5698ab6ea611 - integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::ntest_callback
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/interactive_session/try_reading_pipe_after_child_exit.rs:181:17
[INFO] [stdout]   21:     0x5698ab6e58ca - integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/interactive_session/try_reading_pipe_after_child_exit.rs:44:5
[INFO] [stdout]   22:     0x5698ab6fda5e - <integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}::{closure#0} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5698ab6f4a26 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   24:     0x5698ab6ac9e2 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   25:     0x5698ab6e357b - __rust_try
[INFO] [stdout]   26:     0x5698ab6ddb86 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   27:     0x5698ab6ddb86 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   28:     0x5698ab6e5913 - integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/interactive_session/try_reading_pipe_after_child_exit.rs:44:5
[INFO] [stdout]   29:     0x5698ab6f88d3 - std[1209cfb42f6d497f]::sys::backtrace::__rust_begin_short_backtrace::<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   30:     0x5698ab69df2b - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   31:     0x5698ab6f47d0 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}, ()>::{closure#1}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   32:     0x5698ab6ac726 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   33:     0x5698ab69f99b - __rust_try
[INFO] [stdout]   34:     0x5698ab69a4f6 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   35:     0x5698ab69a4f6 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   36:     0x5698ab69a4f6 - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   37:     0x5698ab6faefe - <std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit::{closure#0}, ()>::{closure#1} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   38:     0x5698ab7d68df - <alloc[420bb310a727dfd7]::boxed::Box<dyn core[4a92201981c6b77a]::ops::function::FnOnce<(), Output = ()> + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   39:     0x5698ab7d68df - <std[1209cfb42f6d497f]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   40:     0x7c9e35f67aa4 - <unknown>
[INFO] [stdout]   41:     0x7c9e35ff4a64 - clone
[INFO] [stdout]   42:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- interactive_session::slow_reader_thread::tests::slow_reader_thread stdout ----
[INFO] [stdout] Waiting for child to exit...
[INFO] [stdout] 0	114	r
[INFO] [stdout] 1	111	o
[INFO] [stdout] 2	111	o
[INFO] [stdout] 3	116	t
[INFO] [stdout] 4	64	@
[INFO] [stdout] 5	97	a
[INFO] [stdout] 6	49	1
[INFO] [stdout] 7	55	7
[INFO] [stdout] 8	50	2
[INFO] [stdout] 9	49	1
[INFO] [stdout] 10	53	5
[INFO] [stdout] 11	102	f
[INFO] [stdout] 12	51	3
[INFO] [stdout] 13	99	c
[INFO] [stdout] 14	54	6
[INFO] [stdout] 15	53	5
[INFO] [stdout] 16	51	3
[INFO] [stdout] 17	58	:
[INFO] [stdout] 18	126	~
[INFO] [stdout] 19	35	#
[INFO] [stdout] 20	32	 
[INFO] [stdout] collected_output: root@a17215f3c653:~# 
[INFO] [stdout] 
[INFO] [stdout] thread '<unnamed>' (24) panicked at tests/interactive_session/slow_reader_thread.rs:245:17:
[INFO] [stdout] Did not receive child exit signal in time: timed out waiting on channel
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::trace_unsynchronized::<std[1209cfb42f6d497f]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5698ab7d6fda - std[1209cfb42f6d497f]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5698ab7d6fda - <<std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[4a92201981c6b77a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5698ab7ec3aa - <core[4a92201981c6b77a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5698ab7ec3aa - core[4a92201981c6b77a]::fmt::write
[INFO] [stdout]    6:     0x5698ab7dc572 - std[1209cfb42f6d497f]::io::default_write_fmt::<alloc[420bb310a727dfd7]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5698ab7dc572 - <alloc[420bb310a727dfd7]::vec::Vec<u8> as std[1209cfb42f6d497f]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5698ab7b4c5f - <std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5698ab7b4c5f - std[1209cfb42f6d497f]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5698ab7cf0a9 - std[1209cfb42f6d497f]::panicking::default_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5698ab70aacc - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5698ab70aacc - test[59e67a9bc0e119f1]::test_main_inner::<test[59e67a9bc0e119f1]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5698ab7cf322 - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5698ab7cf322 - std[1209cfb42f6d497f]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5698ab7b4d18 - std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5698ab7a9909 - std[1209cfb42f6d497f]::sys::backtrace::__rust_end_short_backtrace::<std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5698ab7b5b1d - __rustc[4effac393e9f3da6]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5698ab7ecb6c - core[4a92201981c6b77a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5698ab6f4300 - integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::ntest_callback
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/interactive_session/slow_reader_thread.rs:245:17
[INFO] [stdout]   20:     0x5698ab6ee9fa - integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/interactive_session/slow_reader_thread.rs:60:5
[INFO] [stdout]   21:     0x5698ab6fda2e - <integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}::{closure#0} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x5698ab6f4a16 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   23:     0x5698ab6ac9c2 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   24:     0x5698ab6e357b - __rust_try
[INFO] [stdout]   25:     0x5698ab6ddb06 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   26:     0x5698ab6ddb06 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   27:     0x5698ab6eefa3 - integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/interactive_session/slow_reader_thread.rs:60:5
[INFO] [stdout]   28:     0x5698ab6f88b3 - std[1209cfb42f6d497f]::sys::backtrace::__rust_begin_short_backtrace::<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   29:     0x5698ab69dd4b - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   30:     0x5698ab6f47a0 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}, ()>::{closure#1}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   31:     0x5698ab6ac6f6 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   32:     0x5698ab69f99b - __rust_try
[INFO] [stdout]   33:     0x5698ab69a126 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   34:     0x5698ab69a126 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   35:     0x5698ab69a126 - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   36:     0x5698ab6faede - <std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::interactive_session::slow_reader_thread::tests::slow_reader_thread::{closure#0}, ()>::{closure#1} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   37:     0x5698ab7d68df - <alloc[420bb310a727dfd7]::boxed::Box<dyn core[4a92201981c6b77a]::ops::function::FnOnce<(), Output = ()> + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   38:     0x5698ab7d68df - <std[1209cfb42f6d497f]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   39:     0x7c9e35f67aa4 - <unknown>
[INFO] [stdout]   40:     0x7c9e35ff4a64 - clone
[INFO] [stdout]   41:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- oneshot_command::test_kill::tests::test_wait_before_kill stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread '<unnamed>' (34) panicked at src/test_helpers.rs:94:19:
[INFO] [stdout] Timeout waiting for shell prompt
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::trace_unsynchronized::<std[1209cfb42f6d497f]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5698ab7d6fda - std[1209cfb42f6d497f]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5698ab7d6fda - <<std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[4a92201981c6b77a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5698ab7ec3aa - <core[4a92201981c6b77a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5698ab7ec3aa - core[4a92201981c6b77a]::fmt::write
[INFO] [stdout]    6:     0x5698ab7dc572 - std[1209cfb42f6d497f]::io::default_write_fmt::<alloc[420bb310a727dfd7]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5698ab7dc572 - <alloc[420bb310a727dfd7]::vec::Vec<u8> as std[1209cfb42f6d497f]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5698ab7b4c5f - <std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5698ab7b4c5f - std[1209cfb42f6d497f]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5698ab7cf0a9 - std[1209cfb42f6d497f]::panicking::default_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5698ab70aacc - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5698ab70aacc - test[59e67a9bc0e119f1]::test_main_inner::<test[59e67a9bc0e119f1]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5698ab7cf322 - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5698ab7cf322 - std[1209cfb42f6d497f]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5698ab7b4d4a - std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x5698ab7a9909 - std[1209cfb42f6d497f]::sys::backtrace::__rust_end_short_backtrace::<std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5698ab7b5b1d - __rustc[4effac393e9f3da6]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5698ab7ecb6c - core[4a92201981c6b77a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5698ab7730d5 - portable_pty[d093ec7e6606166a]::test_helpers::setup_shell_session
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test_helpers.rs:94:19
[INFO] [stdout]   20:     0x5698ab6b44e2 - integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::ntest_callback
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_kill.rs:26:29
[INFO] [stdout]   21:     0x5698ab6ad63a - integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_kill.rs:24:5
[INFO] [stdout]   22:     0x5698ab6fd99e - <integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}::{closure#0} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5698ab6f49e6 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   24:     0x5698ab6ac962 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   25:     0x5698ab6e357b - __rust_try
[INFO] [stdout]   26:     0x5698ab6dd986 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   27:     0x5698ab6dd986 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   28:     0x5698ab6adbe3 - integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_kill.rs:24:5
[INFO] [stdout]   29:     0x5698ab6f8853 - std[1209cfb42f6d497f]::sys::backtrace::__rust_begin_short_backtrace::<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   30:     0x5698ab69d7ab - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   31:     0x5698ab6f4710 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}, ()>::{closure#1}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   32:     0x5698ab6ac666 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   33:     0x5698ab69f99b - __rust_try
[INFO] [stdout]   34:     0x5698ab6995b6 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   35:     0x5698ab6995b6 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   36:     0x5698ab6995b6 - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   37:     0x5698ab6fae7e - <std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_wait_before_kill::{closure#0}, ()>::{closure#1} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   38:     0x5698ab7d68df - <alloc[420bb310a727dfd7]::boxed::Box<dyn core[4a92201981c6b77a]::ops::function::FnOnce<(), Output = ()> + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   39:     0x5698ab7d68df - <std[1209cfb42f6d497f]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   40:     0x7c9e35f67aa4 - <unknown>
[INFO] [stdout]   41:     0x7c9e35ff4a64 - clone
[INFO] [stdout]   42:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- oneshot_command::test_kill::tests::test_kill stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread '<unnamed>' (32) panicked at src/test_helpers.rs:94:19:
[INFO] [stdout] Timeout waiting for shell prompt
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::trace_unsynchronized::<std[1209cfb42f6d497f]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5698ab7d6fda - std[1209cfb42f6d497f]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5698ab7d6fda - <<std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[4a92201981c6b77a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5698ab7ec3aa - <core[4a92201981c6b77a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5698ab7ec3aa - core[4a92201981c6b77a]::fmt::write
[INFO] [stdout]    6:     0x5698ab7dc572 - std[1209cfb42f6d497f]::io::default_write_fmt::<alloc[420bb310a727dfd7]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5698ab7dc572 - <alloc[420bb310a727dfd7]::vec::Vec<u8> as std[1209cfb42f6d497f]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5698ab7b4c5f - <std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5698ab7b4c5f - std[1209cfb42f6d497f]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5698ab7cf0a9 - std[1209cfb42f6d497f]::panicking::default_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5698ab70aacc - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5698ab70aacc - test[59e67a9bc0e119f1]::test_main_inner::<test[59e67a9bc0e119f1]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5698ab7cf322 - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5698ab7cf322 - std[1209cfb42f6d497f]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5698ab7b4d4a - std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x5698ab7a9909 - std[1209cfb42f6d497f]::sys::backtrace::__rust_end_short_backtrace::<std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5698ab7b5b1d - __rustc[4effac393e9f3da6]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5698ab7ecb6c - core[4a92201981c6b77a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5698ab7730d5 - portable_pty[d093ec7e6606166a]::test_helpers::setup_shell_session
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test_helpers.rs:94:19
[INFO] [stdout]   20:     0x5698ab6b55b2 - integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::ntest_callback
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_kill.rs:9:29
[INFO] [stdout]   21:     0x5698ab6ad65a - integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_kill.rs:7:5
[INFO] [stdout]   22:     0x5698ab6fd9fe - <integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}::{closure#0} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5698ab6f4a06 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   24:     0x5698ab6ac9a2 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   25:     0x5698ab6e357b - __rust_try
[INFO] [stdout]   26:     0x5698ab6dda86 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   27:     0x5698ab6dda86 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   28:     0x5698ab6add03 - integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_kill.rs:7:5
[INFO] [stdout]   29:     0x5698ab6f8893 - std[1209cfb42f6d497f]::sys::backtrace::__rust_begin_short_backtrace::<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   30:     0x5698ab69db6b - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   31:     0x5698ab6f4770 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}, ()>::{closure#1}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   32:     0x5698ab6ac6c6 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   33:     0x5698ab69f99b - __rust_try
[INFO] [stdout]   34:     0x5698ab699d56 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   35:     0x5698ab699d56 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   36:     0x5698ab699d56 - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   37:     0x5698ab6faebe - <std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill::{closure#0}, ()>::{closure#1} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   38:     0x5698ab7d68df - <alloc[420bb310a727dfd7]::boxed::Box<dyn core[4a92201981c6b77a]::ops::function::FnOnce<(), Output = ()> + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   39:     0x5698ab7d68df - <std[1209cfb42f6d497f]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   40:     0x7c9e35f67aa4 - <unknown>
[INFO] [stdout]   41:     0x7c9e35ff4a64 - clone
[INFO] [stdout]   42:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- oneshot_command::test_kill::tests::test_kill_return_value stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread '<unnamed>' (36) panicked at src/test_helpers.rs:94:19:
[INFO] [stdout] Timeout waiting for shell prompt
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::trace_unsynchronized::<std[1209cfb42f6d497f]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5698ab7d6fda - std[1209cfb42f6d497f]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5698ab7d6fda - <<std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[4a92201981c6b77a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5698ab7ec3aa - <core[4a92201981c6b77a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5698ab7ec3aa - core[4a92201981c6b77a]::fmt::write
[INFO] [stdout]    6:     0x5698ab7dc572 - std[1209cfb42f6d497f]::io::default_write_fmt::<alloc[420bb310a727dfd7]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5698ab7dc572 - <alloc[420bb310a727dfd7]::vec::Vec<u8> as std[1209cfb42f6d497f]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5698ab7b4c5f - <std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5698ab7b4c5f - std[1209cfb42f6d497f]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5698ab7cf0a9 - std[1209cfb42f6d497f]::panicking::default_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5698ab70aacc - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5698ab70aacc - test[59e67a9bc0e119f1]::test_main_inner::<test[59e67a9bc0e119f1]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5698ab7cf322 - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5698ab7cf322 - std[1209cfb42f6d497f]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5698ab7b4d4a - std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x5698ab7a9909 - std[1209cfb42f6d497f]::sys::backtrace::__rust_end_short_backtrace::<std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5698ab7b5b1d - __rustc[4effac393e9f3da6]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5698ab7ecb6c - core[4a92201981c6b77a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5698ab7730d5 - portable_pty[d093ec7e6606166a]::test_helpers::setup_shell_session
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test_helpers.rs:94:19
[INFO] [stdout]   20:     0x5698ab6b4fd2 - integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::ntest_callback
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_kill.rs:73:29
[INFO] [stdout]   21:     0x5698ab6ad64a - integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_kill.rs:71:5
[INFO] [stdout]   22:     0x5698ab6fd9ce - <integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}::{closure#0} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x5698ab6f49f6 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   24:     0x5698ab6ac982 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   25:     0x5698ab6e357b - __rust_try
[INFO] [stdout]   26:     0x5698ab6dda06 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   27:     0x5698ab6dda06 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   28:     0x5698ab6adc73 - integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_kill.rs:71:5
[INFO] [stdout]   29:     0x5698ab6f8873 - std[1209cfb42f6d497f]::sys::backtrace::__rust_begin_short_backtrace::<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   30:     0x5698ab69d98b - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   31:     0x5698ab6f4740 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}, ()>::{closure#1}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   32:     0x5698ab6ac696 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   33:     0x5698ab69f99b - __rust_try
[INFO] [stdout]   34:     0x5698ab699986 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   35:     0x5698ab699986 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   36:     0x5698ab699986 - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   37:     0x5698ab6fae9e - <std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_kill::tests::test_kill_return_value::{closure#0}, ()>::{closure#1} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   38:     0x5698ab7d68df - <alloc[420bb310a727dfd7]::boxed::Box<dyn core[4a92201981c6b77a]::ops::function::FnOnce<(), Output = ()> + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   39:     0x5698ab7d68df - <std[1209cfb42f6d497f]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   40:     0x7c9e35f67aa4 - <unknown>
[INFO] [stdout]   41:     0x7c9e35ff4a64 - clone
[INFO] [stdout]   42:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress stdout ----
[INFO] [stdout] Iteration 0 timed out (>5000ms)
[INFO] [stdout] Iteration 1 timed out (>5000ms)
[INFO] [stdout] Iteration 2 timed out (>5000ms)
[INFO] [stdout] Iteration 3 timed out (>5000ms)
[INFO] [stdout] Iteration 4 timed out (>5000ms)
[INFO] [stdout] Iteration 5 timed out (>5000ms)
[INFO] [stdout] Iteration 6 timed out (>5000ms)
[INFO] [stdout] Iteration 7 timed out (>5000ms)
[INFO] [stdout] Iteration 8 timed out (>5000ms)
[INFO] [stdout] Iteration 9 timed out (>5000ms)
[INFO] [stdout] Iteration 10 timed out (>5000ms)
[INFO] [stdout] Iteration 11 timed out (>5000ms)
[INFO] [stdout] Iteration 12 timed out (>5000ms)
[INFO] [stdout] Iteration 13 timed out (>5000ms)
[INFO] [stdout] Iteration 14 timed out (>5000ms)
[INFO] [stdout] Iteration 15 timed out (>5000ms)
[INFO] [stdout] Iteration 16 timed out (>5000ms)
[INFO] [stdout] Iteration 17 timed out (>5000ms)
[INFO] [stdout] Iteration 18 timed out (>5000ms)
[INFO] [stdout] Iteration 19 timed out (>5000ms)
[INFO] [stdout] Iteration 20 timed out (>5000ms)
[INFO] [stdout] Iteration 21 timed out (>5000ms)
[INFO] [stdout] Iteration 22 timed out (>5000ms)
[INFO] [stdout] Iteration 23 timed out (>5000ms)
[INFO] [stdout] Iteration 24 timed out (>5000ms)
[INFO] [stdout] Iteration 25 timed out (>5000ms)
[INFO] [stdout] Iteration 26 timed out (>5000ms)
[INFO] [stdout] Iteration 27 timed out (>5000ms)
[INFO] [stdout] Iteration 28 timed out (>5000ms)
[INFO] [stdout] Iteration 29 timed out (>5000ms)
[INFO] [stdout] Iteration 30 timed out (>5000ms)
[INFO] [stdout] Iteration 31 timed out (>5000ms)
[INFO] [stdout] Iteration 32 timed out (>5000ms)
[INFO] [stdout] Iteration 33 timed out (>5000ms)
[INFO] [stdout] Iteration 34 timed out (>5000ms)
[INFO] [stdout] Iteration 35 timed out (>5000ms)
[INFO] [stdout] Iteration 36 timed out (>5000ms)
[INFO] [stdout] Iteration 37 timed out (>5000ms)
[INFO] [stdout] Iteration 38 timed out (>5000ms)
[INFO] [stdout] Iteration 39 timed out (>5000ms)
[INFO] [stdout] Iteration 40 timed out (>5000ms)
[INFO] [stdout] Iteration 41 timed out (>5000ms)
[INFO] [stdout] Iteration 42 timed out (>5000ms)
[INFO] [stdout] Iteration 43 timed out (>5000ms)
[INFO] [stdout] Iteration 44 timed out (>5000ms)
[INFO] [stdout] Iteration 45 timed out (>5000ms)
[INFO] [stdout] Iteration 46 timed out (>5000ms)
[INFO] [stdout] Iteration 47 timed out (>5000ms)
[INFO] [stdout] Iteration 48 timed out (>5000ms)
[INFO] [stdout] Iteration 49 timed out (>5000ms)
[INFO] [stdout] Completed 0 iterations (50 failures, 0 slow >5000ms) in 5000ms (avg 100.00ms/iter)
[INFO] [stdout] 
[INFO] [stdout] thread '<unnamed>' (35) panicked at tests/oneshot_command/test_wait_before_kill_stress.rs:140:9:
[INFO] [stdout] assertion `left == right` failed: Some iterations failed
[INFO] [stdout]   left: 0
[INFO] [stdout]  right: 50
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5698ab7d6fda - std[1209cfb42f6d497f]::backtrace_rs::backtrace::trace_unsynchronized::<std[1209cfb42f6d497f]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5698ab7d6fda - std[1209cfb42f6d497f]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5698ab7d6fda - <<std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[4a92201981c6b77a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5698ab7ec3aa - <core[4a92201981c6b77a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5698ab7ec3aa - core[4a92201981c6b77a]::fmt::write
[INFO] [stdout]    6:     0x5698ab7dc572 - std[1209cfb42f6d497f]::io::default_write_fmt::<alloc[420bb310a727dfd7]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5698ab7dc572 - <alloc[420bb310a727dfd7]::vec::Vec<u8> as std[1209cfb42f6d497f]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5698ab7b4c5f - <std[1209cfb42f6d497f]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5698ab7b4c5f - std[1209cfb42f6d497f]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5698ab7cf0a9 - std[1209cfb42f6d497f]::panicking::default_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5698ab70aacc - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5698ab70aacc - test[59e67a9bc0e119f1]::test_main_inner::<test[59e67a9bc0e119f1]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5698ab7cf322 - <alloc[420bb310a727dfd7]::boxed::Box<dyn for<'a, 'b> core[4a92201981c6b77a]::ops::function::Fn<(&'a std[1209cfb42f6d497f]::panic::PanicHookInfo<'b>,), Output = ()> + core[4a92201981c6b77a]::marker::Sync + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::Fn<(&std[1209cfb42f6d497f]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5698ab7cf322 - std[1209cfb42f6d497f]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5698ab7b4d18 - std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5698ab7a9909 - std[1209cfb42f6d497f]::sys::backtrace::__rust_end_short_backtrace::<std[1209cfb42f6d497f]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5698ab7b5b1d - __rustc[4effac393e9f3da6]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5698ab7ecb6c - core[4a92201981c6b77a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5698ab7eca83 - core[4a92201981c6b77a]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x5698ab7e88cd - core[4a92201981c6b77a]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x5698ab6b27ce - integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::ntest_callback
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_wait_before_kill_stress.rs:140:9
[INFO] [stdout]   22:     0x5698ab6ad61a - integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_wait_before_kill_stress.rs:61:5
[INFO] [stdout]   23:     0x5698ab6fd93e - <integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}::{closure#0} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5698ab6f49c6 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   25:     0x5698ab6ac922 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   26:     0x5698ab6e357b - __rust_try
[INFO] [stdout]   27:     0x5698ab6dd886 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x5698ab6dd886 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x5698ab6ada03 - integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/oneshot_command/test_wait_before_kill_stress.rs:61:5
[INFO] [stdout]   30:     0x5698ab6f8813 - std[1209cfb42f6d497f]::sys::backtrace::__rust_begin_short_backtrace::<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   31:     0x5698ab69d3eb - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   32:     0x5698ab6f46b0 - <core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}, ()>::{closure#1}::{closure#0}> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   33:     0x5698ab6ac606 - std[1209cfb42f6d497f]::panicking::catch_unwind::do_call::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:581:40
[INFO] [stdout]   34:     0x5698ab69f99b - __rust_try
[INFO] [stdout]   35:     0x5698ab698e16 - std[1209cfb42f6d497f]::panicking::catch_unwind::<(), core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panicking.rs:544:19
[INFO] [stdout]   36:     0x5698ab698e16 - std[1209cfb42f6d497f]::panic::catch_unwind::<core[4a92201981c6b77a]::panic::unwind_safe::AssertUnwindSafe<std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/panic.rs:359:14
[INFO] [stdout]   37:     0x5698ab698e16 - std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked::<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   38:     0x5698ab6fae3e - <std[1209cfb42f6d497f]::thread::lifecycle::spawn_unchecked<integration[dd4129d3bc39802]::oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress::{closure#0}, ()>::{closure#1} as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   39:     0x5698ab7d68df - <alloc[420bb310a727dfd7]::boxed::Box<dyn core[4a92201981c6b77a]::ops::function::FnOnce<(), Output = ()> + core[4a92201981c6b77a]::marker::Send> as core[4a92201981c6b77a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   40:     0x5698ab7d68df - <std[1209cfb42f6d497f]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/f9988fefd3add01f414f52b414308e7872622fee/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   41:     0x7c9e35f67aa4 - <unknown>
[INFO] [stdout]   42:     0x7c9e35ff4a64 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     interactive_session::slow_reader_thread::tests::slow_reader_thread
[INFO] [stdout]     interactive_session::try_reading_pipe_after_child_exit::tests::try_reading_pipe_after_child_exit
[INFO] [stdout]     oneshot_command::test_kill::tests::test_kill
[INFO] [stdout]     oneshot_command::test_kill::tests::test_kill_return_value
[INFO] [stdout]     oneshot_command::test_kill::tests::test_wait_before_kill
[INFO] [stdout]     oneshot_command::test_wait_before_kill_stress::tests::test_wait_before_kill_stress
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 2 passed; 6 failed; 0 ignored; 0 measured; 0 filtered out; finished in 5.01s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test integration`
[INFO] running `Command { std: "docker" "inspect" "a17215f3c653f51b416faa988685f1b8c46b36dd414577d0640e93cae6a47237", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a17215f3c653f51b416faa988685f1b8c46b36dd414577d0640e93cae6a47237", kill_on_drop: false }`
[INFO] [stdout] a17215f3c653f51b416faa988685f1b8c46b36dd414577d0640e93cae6a47237
